Skip to content
This repository has been archived by the owner on Dec 6, 2023. It is now read-only.

Command with a trigger /remind not found #115

Closed
scottleedavis opened this issue Jun 2, 2019 · 20 comments
Closed

Command with a trigger /remind not found #115

scottleedavis opened this issue Jun 2, 2019 · 20 comments
Labels
Type/Bug Something isn't working

Comments

@scottleedavis
Copy link
Owner

Reposting for @tungle
Hi, suddenly I got this error "Command with a trigger /remind not found". What just happened? (I can still remind myself though, like "/remind me ...." )
report

@tungle
Copy link

tungle commented Jun 3, 2019

@scottleedavis hey, tks. The version with quote still doesn't work, as below. Could you check. One thing I recognized though, if I disable the plugin then re-enable it, it works for a while, then crash again
image

@scottleedavis
Copy link
Owner Author

@tungle could you share the logs when this happens? Also what server and os are you running?

@scottleedavis scottleedavis added the Type/Question Further information is requested label Jun 3, 2019
@scottleedavis
Copy link
Owner Author

I am currently not able to repro given this information, on 5.11 & v0.3.1. Trying to see what might be going on.

@tungle
Copy link

tungle commented Jun 6, 2019

HI @scottleedavis, sorry for late rep.
Mattermost Version: 5.10.0
Database Schema Version: 5.10.0
Database: mysql

Plugin version: 0.1.9.
Am I too far behind on plugin version?

@scottleedavis
Copy link
Owner Author

Try version 0.3.1 and we will go from there?

@jkvd17
Copy link

jkvd17 commented Jun 7, 2019

HI @scottleedavis, I have the same problem.
Server: hyper-v
Os: ubuntu 18.04
Mattermost Version: 5.11.0
Database Schema Version: 5.11.0
Database: mysql

Plugin version: 0.3.1.
In logs:


{"level":"info","ts":1559910365.788396,"caller":"mlog/log.go:164","msg":"Starting up plugins"}
{"level":"error","ts":1559910372.8949358,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"info","ts":1559910373.0145345,"caller":"app/server.go:191","msg":"Current version is 5.11.0 (5.11.0/Wed May 15 19:25:27 UTC 2019/692d1be91eafb64328ce21bcd18671288eb5139b/4ea8989b44bb54a2ccb26d06eb635ed210606313)"}
{"level":"info","ts":1559910373.0151324,"caller":"app/server.go:192","msg":"Enterprise Enabled: true"}
{"level":"info","ts":1559910373.01551,"caller":"app/server.go:194","msg":"Current working directory is /opt/mattermost"}
{"level":"info","ts":1559910373.0158486,"caller":"app/server.go:195","msg":"Loaded config","source":"file:///opt/mattermost/config/config.json"}
{"level":"error","ts":1559910373.0356467,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"info","ts":1559910373.0411584,"caller":"sqlstore/post_store.go:1293","msg":"Post.Message supports at most 16383 characters (65535 bytes)"}
{"level":"error","ts":1559910373.1542373,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"info","ts":1559910373.2256708,"caller":"jobs/workers.go:68","msg":"Starting workers"}
{"level":"info","ts":1559910373.2274022,"caller":"app/server.go:391","msg":"Starting Server..."}
{"level":"info","ts":1559910373.2286112,"caller":"app/server.go:457","msg":"Server is listening on [::]:8065"}
{"level":"info","ts":1559910373.2277365,"caller":"jobs/schedulers.go:72","msg":"Starting schedulers."}
{"level":"info","ts":1559910373.251751,"caller":"app/web_hub.go:75","msg":"Starting 4 websocket hubs"}
{"level":"info","ts":1559910373.3322468,"caller":"commands/server.go:105","msg":"Sending systemd READY notification."}
{"level":"info","ts":1559910420.9433272,"caller":"analytics-go/analytics.go:263","msg":"error sending request: Post https://api.segment.io/v1/batch: dial tcp: lookup api.segment.io: Temporary failure in name resolution","source":"segment"}
{"level":"info","ts":1559910448.0584872,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"4y6crbdheprexee9msgxmssgho"}
{"level":"info","ts":1559910508.1995707,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"egy6enuch3b43r695bibdsebme"}
{"level":"error","ts":1559910552.6260436,"caller":"mlog/log.go:172","msg":"Unable to install plugin. A plugin with the same ID is already installed.","path":"/api/v4/plugins","request_id":"3q6rsonyuirgmy5pp8kje48kbw","ip_addr":"192.168.2.160","user_id":"srmodsaarp8kxe3dmto18kbsiy","method":"POST","err_where":"installPlugin","http_code":400,"err_details":""}
{"level":"error","ts":1559910556.3494182,"caller":"mlog/log.go:172","msg":"RPC call OnDeactivate to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"warn","ts":1559910556.350344,"caller":"plugin/hclog_adapter.go:50","msg":"error closing client during Kill","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"errconnection is shut down"}
{"level":"error","ts":1559910557.9936426,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1559910557.9979146,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910558.1538942,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910562.5268376,"caller":"mlog/log.go:172","msg":"RPC call OnDeactivate to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"warn","ts":1559910562.5269673,"caller":"plugin/hclog_adapter.go:50","msg":"error closing client during Kill","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"errconnection is shut down"}
{"level":"error","ts":1559910563.6913087,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1559910563.6932673,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910563.8085911,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"info","ts":1559910568.23155,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"bi3m1w8c3pd77bebfke6bfcbta"}
{"level":"error","ts":1559910589.0514765,"caller":"mlog/log.go:172","msg":"RPC call OnDeactivate to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"warn","ts":1559910589.053018,"caller":"plugin/hclog_adapter.go:50","msg":"error closing client during Kill","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"errconnection is shut down"}
{"level":"error","ts":1559910598.3685212,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1559910598.3705616,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910598.3911803,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910605.2786775,"caller":"mlog/log.go:172","msg":"RPC call OnDeactivate to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"warn","ts":1559910605.2787905,"caller":"plugin/hclog_adapter.go:50","msg":"error closing client during Kill","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"errconnection is shut down"}
{"level":"error","ts":1559910606.365392,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1559910606.3661854,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910606.3906424,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910624.197765,"caller":"mlog/log.go:172","msg":"RPC call OnDeactivate to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"warn","ts":1559910624.197902,"caller":"plugin/hclog_adapter.go:50","msg":"error closing client during Kill","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"errconnection is shut down"}
{"level":"error","ts":1559910634.8187604,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1559910634.825328,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1559910634.836511,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"info","ts":1559910703.4372933,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"kqmtkx3eqjgc3r84ohaqkeohmh"}
{"level":"info","ts":1559910763.5284219,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"w1h4d1a1tbd1zdjh94pzo8ff5w"}
{"level":"info","ts":1559910823.6190152,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"7dh3i3szxbfytkgw9t4du8cdxa"}
{"level":"info","ts":1559910883.6924007,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"b8ip1kmusb8s9foekp1gmgsure"}
{"level":"info","ts":1559910943.7914026,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"7t7m7bcphjr3pe4371bgrfs7ac"}
{"level":"info","ts":1559911003.848505,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"byedj945utnqdgd1efkk68ihzh"}
{"level":"info","ts":1559911063.9313095,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"tnchu6qedjdk8gz7y4cf4j413e"}
{"level":"info","ts":1559911124.0215364,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"5qpmng7jutrz9rpo6jph5utc3o"}
{"level":"info","ts":1559911184.1625078,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"4w7m8jisx7fd8rf889dr6eb73c"}
{"level":"info","ts":1559911244.2027643,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"hr8ino5mm7rndydg7rso91amde"}
{"level":"info","ts":1559911304.2852414,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"9r6z31z7rtr49d1p8qmkj93r8o"}

@scottleedavis
Copy link
Owner Author

@jkvd17 & @tungle
Could either or both of you try the following release?
https://github.com/scottleedavis/mattermost-plugin-remind/releases/tag/v0.3.1.issue_115

It has logging in the OnActivate function, you should see

INFO[2019-06-07T08:55:01.927221-07:00] checkServerVersion                            caller="mlog/sugar.go:19" plugin_id=com.github.scottleedavis.mattermost-plugin-remind
INFO[2019-06-07T08:55:01.9276428-07:00] GetTeams                                      caller="mlog/sugar.go:19" plugin_id=com.github.scottleedavis.mattermost-plugin-remind
INFO[2019-06-07T08:55:01.9297311-07:00] InitAPI                                       caller="mlog/sugar.go:19" plugin_id=com.github.scottleedavis.mattermost-plugin-remind
INFO[2019-06-07T08:55:01.930186-07:00] ensureBotExists                               caller="mlog/sugar.go:19" plugin_id=com.github.scottleedavis.mattermost-plugin-remind
INFO[2019-06-07T08:55:01.942975-07:00] registerCommand                               caller="mlog/sugar.go:19" plugin_id=com.github.scottleedavis.mattermost-plugin-remind
INFO[2019-06-07T08:55:01.943427-07:00] Run                                           caller="mlog/sugar.go:19" plugin_id=com.github.scottleedavis.mattermost-plugin-remind

if anything is missing that will help to identify where the issue might be.

@jkvd17
Copy link

jkvd17 commented Jun 7, 2019

Well, on Monday I'll try this version.
In version 0.3.1, after installation, the bot does not appear in the user list.

@jkvd17
Copy link

jkvd17 commented Jun 10, 2019

Install https://github.com/scottleedavis/mattermost-plugin-remind/releases/tag/v0.3.1.issue_115
Logs:


{"level":"error","ts":1560149171.2524133,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1560149171.271516,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1560149171.324643,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"info","ts":1560149243.7134197,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"o3q6gkskwib7uphztmhfx9e3wy"}
{"level":"error","ts":1560149244.034658,"caller":"mlog/log.go:172","msg":"RPC call OnDeactivate to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"warn","ts":1560149244.034764,"caller":"plugin/hclog_adapter.go:50","msg":"error closing client during Kill","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"errconnection is shut down"}
{"level":"error","ts":1560149245.40812,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1560149245.4266,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1560149245.4552875,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}

@scottleedavis scottleedavis added Type/Bug Something isn't working and removed Type/Question Further information is requested labels Jun 11, 2019
@scottleedavis
Copy link
Owner Author

@tungle is your mattermost install's siteURL set?

@scottleedavis
Copy link
Owner Author

@jkvd17 I setup a vmware + ubuntu 18.04 + mattermost 5.11 install, and could not replicate your error. Another mattermost user in the community developers channel had this exact same error. I am still trying to replicate it.

@tungle
Copy link

tungle commented Jun 12, 2019

@tungle is your mattermost install's siteURL set?

@scottleedavis after upgrading to version 0.3.1 it's all good for me now. Thanks

@scottleedavis
Copy link
Owner Author

@jkvd17 I am sorry this isn't working. On recommendation, I setup logging not through the plugin API to see what is going wrong. Could you try this logging version just updated please?
https://github.com/scottleedavis/mattermost-plugin-remind/releases/tag/v0.3.2.issue_115

you should see output like

INFO[2019-06-12T09:23:03.954844-07:00] REMIND: OnConfigurationChange                 caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.954902-07:00] REMIND: GetConfig                             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.956488-07:00] REMIND: TranslationsPreInit                   caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.957772-07:00] REMIND: end OnConfigurationChange             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.957802-07:00] REMIND: OnActivate                            caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.957815-07:00] REMIND: checkServerVersion                    caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.957943-07:00] REMIND: GetTeams                              caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.9594371-07:00] REMIND: InitAPI                               caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.959627-07:00] REMIND: ensureBotExists                       caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.969961-07:00] REMIND: registerCommand                       caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.9702551-07:00] REMIND: Run                                   caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.970287-07:00] REMIND: end OnActivate                        caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.971141-07:00] REMIND: OnConfigurationChange                 caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.971175-07:00] REMIND: GetConfig                             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.9717739-07:00] REMIND: TranslationsPreInit                   caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.972893-07:00] REMIND: end OnConfigurationChange             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.989068-07:00] REMIND: OnConfigurationChange                 caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.98911-07:00] REMIND: GetConfig                             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.98972-07:00] REMIND: TranslationsPreInit                   caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:03.990928-07:00] REMIND: end OnConfigurationChange             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.0277078-07:00] REMIND: OnConfigurationChange                 caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.027767-07:00] REMIND: GetConfig                             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.0284202-07:00] REMIND: TranslationsPreInit                   caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.03029-07:00] REMIND: end OnConfigurationChange             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.050188-07:00] REMIND: OnConfigurationChange                 caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.050229-07:00] REMIND: GetConfig                             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.050893-07:00] REMIND: TranslationsPreInit                   caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout
INFO[2019-06-12T09:23:04.052045-07:00] REMIND: end OnConfigurationChange             caller="go-plugin/stream.go:15" plugin_id=com.github.scottleedavis.mattermost-plugin-remind source=plugin_stdout

@jkvd17
Copy link

jkvd17 commented Jun 12, 2019

@scottleedavis, thanks, i install ver. 0.3.2. Send logs on Thursday.

@scottleedavis
Copy link
Owner Author

posted by @sapnasivakumar image

a place of 'where' seems determined. curious to know if it is the same place/fix for yours @jkvd17 .

@scottleedavis
Copy link
Owner Author

also, do you have a siteURL set in config?

@jkvd17
Copy link

jkvd17 commented Jun 13, 2019

@scottleedavis, siteURL is not set in config.
Logs from ver. 0.3.2

{"level":"info","ts":1560409260.6738114,"caller":"go-plugin/stream.go:15","msg":"REMIND: OnConfigurationChange","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","source":"plugin_stdout"}
{"level":"info","ts":1560409260.6740112,"caller":"go-plugin/stream.go:15","msg":"REMIND: GetConfig","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","source":"plugin_stdout"}
{"level":"error","ts":1560409260.6850522,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1560409260.697891,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"error","ts":1560409260.7317314,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"info","ts":1560409332.9870844,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"i73ojwhnmbnkjxbgibnqxe53ar"}
{"level":"info","ts":1560409393.1111243,"caller":"scheduler/worker.go:78","msg":"Worker: Job is complete","worker":"Plugins","job_id":"qpza4w66htd7ip8dxiwi8hcaar"}
{"level":"error","ts":1560409412.7433195,"caller":"mlog/log.go:172","msg":"RPC call OnDeactivate to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"warn","ts":1560409412.744432,"caller":"plugin/hclog_adapter.go:50","msg":"error closing client during Kill","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"errconnection is shut down"}
{"level":"debug","ts":1560409426.8141391,"caller":"jobs/schedulers.go:167","msg":"Next run time for scheduler PluginsScheduler: 2019-06-13 07:04:46.8141175 +0000 UTC m=+57162.458044101"}
{"level":"debug","ts":1560409433.2626,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409433.4025016,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409437.288321,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409437.5511773,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409441.4790287,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409441.6975455,"caller":"web/handlers.go:58","msg":"GET - /api/v4/plugins/statuses"}
{"level":"debug","ts":1560409447.0613053,"caller":"web/handlers.go:58","msg":"POST - /api/v4/plugins/com.github.scottleedavis.mattermost-plugin-remind/enable"}
{"level":"debug","ts":1560409447.0694468,"caller":"jobs/schedulers.go:185","msg":"Schedulers received config change."}
{"level":"debug","ts":1560409447.0738382,"caller":"jobs/schedulers.go:167","msg":"Next run time for scheduler MigrationsScheduler: "}
{"level":"debug","ts":1560409447.0812418,"caller":"plugin/hclog_adapter.go:32","msg":"starting plugin","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"pathplugins/com.github.scottleedavis.mattermost-plugin-remind/server/dist/plugin-linux-amd64args[plugins/com.github.scottleedavis.mattermost-plugin-remind/server/dist/plugin-linux-amd64]"}
{"level":"debug","ts":1560409447.0819569,"caller":"plugin/hclog_adapter.go:32","msg":"plugin started","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"pathplugins/com.github.scottleedavis.mattermost-plugin-remind/server/dist/plugin-linux-amd64pid2524"}
{"level":"debug","ts":1560409447.0820363,"caller":"plugin/hclog_adapter.go:32","msg":"waiting for RPC address","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"pathplugins/com.github.scottleedavis.mattermost-plugin-remind/server/dist/plugin-linux-amd64"}
{"level":"debug","ts":1560409447.09816,"caller":"plugin/hclog_adapter.go:32","msg":"plugin address","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"address/tmp/plugin165932939networkunixtimestamp2019-06-13T07:04:07.097Z"}
{"level":"debug","ts":1560409447.0984712,"caller":"plugin/hclog_adapter.go:32","msg":"using plugin","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"version1"}
{"level":"debug","ts":1560409447.1145725,"caller":"plugin/hclog_adapter.go:34","msg":"panic: runtime error: invalid memory address or nil pointer dereference","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1150777,"caller":"plugin/hclog_adapter.go:34","msg":"[signal SIGSEGV: segmentation violation code=0x1 addr=0x0 pc=0x9e3b10]","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1151795,"caller":"plugin/hclog_adapter.go:34","msg":"","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.115458,"caller":"plugin/hclog_adapter.go:34","msg":"goroutine 16 [running]:","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.115887,"caller":"plugin/hclog_adapter.go:34","msg":"main.(*Plugin).OnConfigurationChange(0xc0001925a0, 0xbb6b40, 0xc0001925a0)","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1193955,"caller":"plugin/hclog_adapter.go:34","msg":"\t/Users/scottd/go/src/github.com/scottleedavis/mattermost-plugin-remind/server/activate.go:85 +0xe0","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1201222,"caller":"plugin/hclog_adapter.go:34","msg":"github.com/mattermost/mattermost-server/plugin.(*hooksRPCServer).OnActivate(0xc00000da60, 0xc000023740, 0xc000236100, 0x0, 0x0)","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1206057,"caller":"plugin/hclog_adapter.go:34","msg":"\t/Users/scottd/go/pkg/mod/github.com/mattermost/mattermost-server@v5.11.0+incompatible/plugin/client_rpc.go:207 +0x204","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1218839,"caller":"plugin/hclog_adapter.go:34","msg":"reflect.Value.call(0xc000224300, 0xc00000eae8, 0x13, 0xbba9f1, 0x4, 0xc00007df18, 0x3, 0x3, 0xc000195d00, 0xc0001a28e8, ...)","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.122331,"caller":"plugin/hclog_adapter.go:34","msg":"\t/usr/local/Cellar/go/1.12.5/libexec/src/reflect/value.go:447 +0x461","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1233773,"caller":"plugin/hclog_adapter.go:34","msg":"reflect.Value.Call(0xc000224300, 0xc00000eae8, 0x13, 0xc000041f18, 0x3, 0x3, 0xc0001a28c0, 0xc000041f10, 0xc000041fb8)","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1238024,"caller":"plugin/hclog_adapter.go:34","msg":"\t/usr/local/Cellar/go/1.12.5/libexec/src/reflect/value.go:308 +0xa4","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1249628,"caller":"plugin/hclog_adapter.go:34","msg":"net/rpc.(*service).call(0xc000195f40, 0xc000088d20, 0xc0000235c0, 0xc0000235d0, 0xc0000dae80, 0xc0002265e0, 0xa7ca20, 0xc000023740, 0x16, 0xa7ca60, ...)","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.125371,"caller":"plugin/hclog_adapter.go:34","msg":"\t/usr/local/Cellar/go/1.12.5/libexec/src/net/rpc/server.go:384 +0x14e","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1255937,"caller":"plugin/hclog_adapter.go:34","msg":"created by net/rpc.(*Server).ServeCodec","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"debug","ts":1560409447.1259785,"caller":"plugin/hclog_adapter.go:34","msg":"\t/usr/local/Cellar/go/1.12.5/libexec/src/net/rpc/server.go:481 +0x42b","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind"}
{"level":"error","ts":1560409447.1309047,"caller":"mlog/log.go:172","msg":"RPC call to OnActivate plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"unexpected EOF"}
{"level":"error","ts":1560409447.1352947,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"debug","ts":1560409447.13606,"caller":"jobs/workers.go:108","msg":"Workers received config change."}
{"level":"debug","ts":1560409447.1394982,"caller":"plugin/hclog_adapter.go:32","msg":"plugin process exited","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","wrapped_extras":"pathplugins/com.github.scottleedavis.mattermost-plugin-remind/server/dist/plugin-linux-amd64pid2524errorexit status 2"}
{"level":"debug","ts":1560409447.1689384,"caller":"jobs/workers.go:108","msg":"Workers received config change."}
{"level":"error","ts":1560409447.178536,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"debug","ts":1560409447.180897,"caller":"jobs/schedulers.go:185","msg":"Schedulers received config change."}
{"level":"debug","ts":1560409447.3104737,"caller":"jobs/schedulers.go:167","msg":"Next run time for scheduler PluginsScheduler: 2019-06-13 07:05:07.3104527 +0000 UTC m=+57182.954379401"}
{"level":"debug","ts":1560409447.31318,"caller":"jobs/schedulers.go:167","msg":"Next run time for scheduler MigrationsScheduler: "}
{"level":"debug","ts":1560409447.5364702,"caller":"jobs/schedulers.go:167","msg":"Next run time for scheduler PluginsScheduler: 2019-06-13 07:05:07.5364503 +0000 UTC m=+57183.180377001"}
{"level":"debug","ts":1560409456.0820568,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409462.6429138,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409469.0002484,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409469.10974,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409474.342725,"caller":"web/handlers.go:58","msg":"PUT - /api/v4/config"}
{"level":"debug","ts":1560409474.3605459,"caller":"jobs/schedulers.go:185","msg":"Schedulers received config change."}
{"level":"error","ts":1560409474.3672292,"caller":"mlog/log.go:172","msg":"RPC call OnConfigurationChange to plugin failed.","plugin_id":"com.github.scottleedavis.mattermost-plugin-remind","error":"connection is shut down"}
{"level":"debug","ts":1560409474.3677678,"caller":"jobs/workers.go:108","msg":"Workers received config change."}
{"level":"debug","ts":1560409474.3782322,"caller":"jobs/schedulers.go:167","msg":"Next run time for scheduler MigrationsScheduler: "}
{"level":"debug","ts":1560409474.6205635,"caller":"jobs/schedulers.go:167","msg":"Next run time for scheduler PluginsScheduler: 2019-06-13 07:05:34.6205207 +0000 UTC m=+57210.264447401"}
{"level":"debug","ts":1560409480.5409012,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}
{"level":"debug","ts":1560409482.8705063,"caller":"web/handlers.go:58","msg":"POST - /api/v4/users/status/ids"}

@scottleedavis
Copy link
Owner Author

@jkvd17 SiteURL must be set for the remind plugin to work. Thank you for sharing logs!

@scottleedavis
Copy link
Owner Author

@jkvd17 https://github.com/scottleedavis/mattermost-plugin-remind/releases/tag/v0.3.3 blocks plugin activation if no siteURL exists. This was the cause of the error.

@jkvd17
Copy link

jkvd17 commented Jun 18, 2019

@scottleedavis, thanks. Plugin work with SiteURL set.

Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
Type/Bug Something isn't working
Projects
None yet
Development

No branches or pull requests

3 participants